[INFO] cloning repository https://github.com/edlz/pokemon-champions-engine
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/edlz/pokemon-champions-engine" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 2310cb6641ee929cc8d7828658d422e79a0dd23a
[INFO] testing edlz/pokemon-champions-engine against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fedlz%2Fpokemon-champions-engine" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/edlz/pokemon-champions-engine
[INFO] finished tweaking git repo https://github.com/edlz/pokemon-champions-engine
[INFO] tweaked toml for git repo https://github.com/edlz/pokemon-champions-engine written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/edlz/pokemon-champions-engine on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/edlz/pokemon-champions-engine already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 97d215f6a42d77a5852e696c2159a2205460fc69c8fce5b09b71c521f7181442
[INFO] running `Command { std: "docker" "start" "-a" "97d215f6a42d77a5852e696c2159a2205460fc69c8fce5b09b71c521f7181442", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "97d215f6a42d77a5852e696c2159a2205460fc69c8fce5b09b71c521f7181442", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "97d215f6a42d77a5852e696c2159a2205460fc69c8fce5b09b71c521f7181442", kill_on_drop: false }`
[INFO] [stdout] 97d215f6a42d77a5852e696c2159a2205460fc69c8fce5b09b71c521f7181442
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 319deb345357779760021a6ce4398712875020137da693a4810becdfd442c8f0
[INFO] running `Command { std: "docker" "start" "-a" "319deb345357779760021a6ce4398712875020137da693a4810becdfd442c8f0", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling rustc-hash v2.1.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling champions-engine v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 24.80s
[INFO] running `Command { std: "docker" "inspect" "319deb345357779760021a6ce4398712875020137da693a4810becdfd442c8f0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "319deb345357779760021a6ce4398712875020137da693a4810becdfd442c8f0", kill_on_drop: false }`
[INFO] [stdout] 319deb345357779760021a6ce4398712875020137da693a4810becdfd442c8f0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 25c6003f3cf461dea6145ad9197b474a4c4142e658e342d2e2526e7285c47ae3
[INFO] running `Command { std: "docker" "start" "-a" "25c6003f3cf461dea6145ad9197b474a4c4142e658e342d2e2526e7285c47ae3", kill_on_drop: false }`
[INFO] [stderr]    Compiling champions-engine v1.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 22.46s
[INFO] running `Command { std: "docker" "inspect" "25c6003f3cf461dea6145ad9197b474a4c4142e658e342d2e2526e7285c47ae3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "25c6003f3cf461dea6145ad9197b474a4c4142e658e342d2e2526e7285c47ae3", kill_on_drop: false }`
[INFO] [stdout] 25c6003f3cf461dea6145ad9197b474a4c4142e658e342d2e2526e7285c47ae3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 0a84a9d775eba306e0ed8a7ec5766da7613b3e208df24b818f44e9020a355a98
[INFO] running `Command { std: "docker" "start" "-a" "0a84a9d775eba306e0ed8a7ec5766da7613b3e208df24b818f44e9020a355a98", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.41s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/champions_engine-12ba33a9d691d861)
[INFO] [stdout] 
[INFO] [stdout] running 155 tests
[INFO] [stdout] test dex::tests::move_index_and_id_lookup_return_same_move ... ok
[INFO] [stdout] test dex::tests::re_registering_move_keeps_stable_index ... ok
[INFO] [stdout] test dex::typechart::tests::all_immunities ... ok
[INFO] [stdout] test dex::typechart::tests::basic_effectiveness ... ok
[INFO] [stdout] test dex::typechart::tests::dual_type_effectiveness ... ok
[INFO] [stdout] test dex::typechart::tests::earthquake_vs_heatran ... ok
[INFO] [stdout] test dex::typechart::tests::fairy_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::fire_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::grass_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::ground_vs_rotom_wash ... ok
[INFO] [stdout] test dex::typechart::tests::fighting_super_effective ... ok
[INFO] [stdout] test dex::typechart::tests::ice_beam_vs_garchomp ... ok
[INFO] [stdout] test dex::typechart::tests::stealth_rock_damage_tiers ... ok
[INFO] [stdout] test dex::typechart::tests::thunderbolt_vs_gyarados ... ok
[INFO] [stdout] test dex::typechart::tests::unknown_type_is_neutral ... ok
[INFO] [stdout] test dex::typechart::tests::water_super_effective ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_force_max_collapses_to_compressed_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_no_ko_zero_crit_returns_three_buckets_summing_to_one ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_with_crit_adds_crit_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_guaranteed_ko_returns_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_guaranteed_ko_returns_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::bucketed_partial_ko_threshold_splits_buckets ... ok
[INFO] [stdout] test engine::tests::avg_damage_matches_roll_mean ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_partial_ko_collapses_killing_rolls_into_single_branch ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_with_crit_adds_one_crit_branch ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_normalizes_against_total_above_one ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_handles_zero_total_probability ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_threshold_at_branch_boundary ... ok
[INFO] [stdout] test engine::tests::compressed_cant_ko_branches_on_crit ... ok
[INFO] [stdout] test engine::combat::damage_outcomes::tests::full_no_ko_zero_crit_enumerates_unique_rolls ... ok
[INFO] [stdout] test engine::tests::compressed_guaranteed_ko_collapses_to_one_branch ... ok
[INFO] [stdout] test id::tests::empty_id ... ok
[INFO] [stdout] test engine::tests::compressed_spanning_ko_branches_on_kill ... ok
[INFO] [stdout] test engine::tests::partition_rolls_all_kill_when_min_above_hp ... ok
[INFO] [stdout] test engine::tests::deterministic_branch_picker_prefers_ko_over_longer_survive_branch ... ok
[INFO] [stdout] test engine::core::branching::tests::pick_branch_by_unit_empirical_distribution_matches_probabilities ... ok
[INFO] [stdout] test engine::tests::partition_rolls_partial_kill ... ok
[INFO] [stdout] test engine::tests::partition_rolls_no_kill_when_max_below_hp ... ok
[INFO] [stdout] test id::tests::normalizes_names ... ok
[INFO] [stdout] test mcts::action_codec::tests::singles_choice_round_trip_uses_move_slot ... ok
[INFO] [stdout] test mcts::action_codec::tests::formats_labels_without_protocol_strings_in_keys ... ok
[INFO] [stdout] test mcts::action_codec::tests::slot_action_round_trip_preserves_target ... ok
[INFO] [stdout] test legal_actions::tests::doubles_team_preview_emits_90_actions ... ok
[INFO] [stdout] test legal_actions::tests::singles_team_preview_emits_60_actions ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_unsorted ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::doubles_apply_revert_roundtrip ... ok
[INFO] [stdout] test mcts::evaluate::tests::mega_charizard_x_reads_as_fire_dragon_for_matchup ... ok
[INFO] [stdout] test legal_actions::tests::singles_tera_gate_emits_one_variant_per_usable_move ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_wrong_size ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::validation_rejects_duplicate_indices ... ok
[INFO] [stdout] test engine::flow::team_preview::tests::singles_apply_revert_roundtrip ... ok
[INFO] [stdout] test mcts::telemetry::tests::recording_telemetry_captures_batched_events ... ok
[INFO] [stdout] test legal_actions::tests::singles_only_one_mechanic_per_battle_after_use ... ok
[INFO] [stdout] test legal_actions::tests::enumerate_legal_actions_unaffected_by_team_preview_state ... ok
[INFO] [stdout] test legal_actions::tests::doubles_drops_paired_mechanic_combos ... ok
[INFO] [stdout] test legal_actions::tests::switch_enumeration_filters_unbrought ... ok
[INFO] [stdout] test mcts::evaluate::tests::healthier_side_scores_above_half ... ok
[INFO] [stdout] test legal_actions::tests::singles_emits_no_mechanic_variants_with_gates_off ... ok
[INFO] [stdout] test mcts::evaluate::tests::one_mega_per_side_only_first_lead_swaps_types ... ok
[INFO] [stdout] test data_loader::tests::load_format_all_includes_full_gen9_dex_and_mechanic_moves ... ok
[INFO] [stdout] test mcts::evaluate::tests::pick_mega_slot_returns_none_when_no_stones ... ok
[INFO] [stdout] test mcts::evaluate::tests::status_penalty_affects_score ... ok
[INFO] [stdout] test mcts::evaluate::tests::terminal_result_overrides_heuristic_score ... ok
[INFO] [stdout] test mcts::evaluate::tests::team_preview_eval_mirror_stays_near_half ... ok
[INFO] [stdout] test mcts::evaluate::tests::team_preview_eval_favors_offensive_type_advantage ... ok
[INFO] [stdout] test mcts::evaluate::tests::type_matchup_neutral_mirror_stays_at_half ... ok
[INFO] [stdout] test mcts::tests::config_policy_drives_puct_to_hot_arm ... ok
[INFO] [stdout] test mcts::tests::mega_actions_enumerated_and_mcts_round_trips_state ... ok
[INFO] [stdout] test mcts::tests::puct_search_runs_and_restores_state ... ok
[INFO] [stdout] test prng::tests::random_chance_0_1_always_false ... ok
[INFO] [stdout] test mcts::tests::rollout_search_restores_root_state_byte_for_byte ... ok
[INFO] [stdout] test prng::tests::random_chance_1_2_balanced ... ok
[INFO] [stdout] test prng::tests::random_chance_217_256_skewed ... ok
[INFO] [stdout] test prng::tests::random_chance_matches_random_lt ... ok
[INFO] [stdout] test prng::tests::random_range_in_bounds ... ok
[INFO] [stdout] test prng::tests::same_seed_same_sequence ... ok
[INFO] [stdout] test prng::tests::random_chance_1_1_always_true ... ok
[INFO] [stdout] test prng::tests::sample_balanced_over_5 ... ok
[INFO] [stdout] test prng::tests::sample_single_item ... ok
[INFO] [stdout] test prng::tests::seed_roundtrip_gen5 ... ok
[INFO] [stdout] test prng::tests::seed_roundtrip_sodium ... ok
[INFO] [stdout] test prng::tests::shuffle_is_deterministic ... ok
[INFO] [stdout] test prng::tests::shuffle_is_permutation ... ok
[INFO] [stdout] test prng::tests::sample_empty_panics - should panic ... ok
[INFO] [stdout] test state::tests::test_battle_state_json_roundtrip ... ok
[INFO] [stdout] test mcts::tests::max_time_ms_caps_iterations_under_short_budget ... ok
[INFO] [stdout] test state::tests::test_choice_roundtrip ... ok
[INFO] [stdout] test mcts::tests::rollout_search_picks_a_best_action ... ok
[INFO] [stdout] test state::tests::test_effect_state_roundtrip ... ok
[INFO] [stdout] test state::tests::test_normalize_log ... ok
[INFO] [stdout] test state::tests::test_prng_seed_roundtrip ... ok
[INFO] [stdout] test stats::tests::accuracy_multiplier_uses_base_3 ... ok
[INFO] [stdout] test stats::tests::adamant_should_boost_atk_lower_spa ... ok
[INFO] [stdout] test stats::tests::boost_by_should_return_false_at_max ... ok
[INFO] [stdout] test stats::tests::boost_by_should_return_true_when_stats_changed ... ok
[INFO] [stdout] test stats::tests::boosts_should_clamp_to_6 ... ok
[INFO] [stdout] test stats::tests::boosts_should_clamp_to_negative_6 ... ok
[INFO] [stdout] test stats::tests::champions_hp_calculation ... ok
[INFO] [stdout] test stats::tests::champions_pp_calculation ... ok
[INFO] [stdout] test stats::tests::champions_stat_with_nature ... ok
[INFO] [stdout] test stats::tests::default_ivs_are_all_31 ... ok
[INFO] [stdout] test stats::tests::modest_should_boost_spa_lower_atk ... ok
[INFO] [stdout] test stats::tests::natures_should_have_opposite_plus_and_minus ... ok
[INFO] [stdout] test stats::tests::neutral_natures_should_have_no_plus_or_minus ... ok
[INFO] [stdout] test stats::tests::shedinja_hp_should_always_be_1 ... ok
[INFO] [stdout] test mcts::tests::team_preview_search_runs_and_emits_team_choices ... ok
[INFO] [stdout] test stats::tests::standard_hp_calc_at_level_50 ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_negative_boosts ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_positive_boosts ... ok
[INFO] [stdout] test stats::tests::stat_multiplier_zero_is_neutral ... ok
[INFO] [stdout] test stats::tests::stats_table_get_and_set ... ok
[INFO] [stdout] test stats::tests::timid_should_boost_spe_lower_atk ... ok
[INFO] [stdout] test stats::tests::trunc_16_bit ... ok
[INFO] [stdout] test stats::tests::trunc_no_bits_returns_input ... ok
[INFO] [stdout] test team_validator::tests::accepts_level_50_max_ivs_and_legal_evs ... ok
[INFO] [stdout] test stats::tests::standard_atk_calc_at_level_50 ... ok
[INFO] [stdout] test team_validator::tests::rejects_empty_team ... ok
[INFO] [stdout] test team_validator::tests::rejects_evs_above_total_limit ... ok
[INFO] [stdout] test team_validator::tests::rejects_missing_team ... ok
[INFO] [stdout] test team_validator::tests::rejects_non_50_level ... ok
[INFO] [stdout] test team_validator::tests::rejects_non_max_ivs ... ok
[INFO] [stdout] test team_validator::tests::reports_multiple_set_errors ... ok
[INFO] [stdout] test teams::tests::export_and_import_roundtrip ... ok
[INFO] [stdout] test team_validator::tests::rejects_evs_above_per_stat_limit ... ok
[INFO] [stdout] test teams::tests::export_removes_nicknames_when_requested ... ok
[INFO] [stdout] test teams::tests::export_hides_stats_when_requested ... ok
[INFO] [stdout] test teams::tests::export_with_nickname ... ok
[INFO] [stdout] test teams::tests::import_frustration_sets_happiness_zero ... ok
[INFO] [stdout] test teams::tests::import_with_ivs ... ok
[INFO] [stdout] test teams::tests::pack_and_unpack_roundtrip ... ok
[INFO] [stdout] test teams::tests::pack_happiness ... ok
[INFO] [stdout] test teams::tests::pack_multiple_sets ... ok
[INFO] [stdout] test teams::tests::pack_name_strips_non_alnum ... ok
[INFO] [stdout] test teams::tests::import_packed_format_single_line ... ok
[INFO] [stdout] test teams::tests::pack_non_default_ivs ... ok
[INFO] [stdout] test teams::tests::pack_shiny_and_level ... ok
[INFO] [stdout] test teams::tests::pack_tera_type ... ok
[INFO] [stdout] test teams::tests::unpack_empty_returns_none ... ok
[INFO] [stdout] test mcts::tests::duct_search_restores_root_state_byte_for_byte ... ok
[INFO] [stdout] test mcts::tests::time_only_budget_runs_without_iteration_cap ... FAILED
[INFO] [stdout] test mcts::evaluate::tests::type_matchup_favors_offensive_advantage ... ok
[INFO] [stdout] test mcts::value::tests::heuristic_matches_evaluate_function ... ok
[INFO] [stdout] test mcts::tests::duct_search_visits_every_root_action_at_least_once ... ok
[INFO] [stdout] test mcts::tests::doubles_search_runs_and_restores_state ... ok
[INFO] [stdout] test mcts::value::tests::const_evaluator_returns_constant ... ok
[INFO] [stdout] test mcts::tests::telemetry_records_search_lifecycle ... ok
[INFO] [stdout] test state::tests::test_calculate_damage_rolls ... ok
[INFO] [stdout] test test_helpers::tests::replay_gender_n_uses_fixed_genderless_metadata_for_rotom ... ok
[INFO] [stdout] test test_helpers::tests::team_preview_normalizes_mega_forme_declarations ... ok
[INFO] [stdout] test test_helpers::tests::replay_gender_n_defaults_variable_species_to_ps_gender ... ok
[INFO] [stdout] test mcts::tests::config_policy_uniform_matches_no_policy ... ok
[INFO] [stdout] test mcts::tests::ucb1_concentrates_visits_on_promising_actions ... ok
[INFO] [stdout] test state::tests::test_battle_hydration_roundtrip ... ok
[INFO] [stdout] test state::tests::test_doubles_battle_hydration_roundtrip ... ok
[INFO] [stdout] test mcts::value::tests::override_drives_root_action_means ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- mcts::tests::time_only_budget_runs_without_iteration_cap stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'mcts::tests::time_only_budget_runs_without_iteration_cap' (96) panicked at src/mcts.rs:2683:9:
[INFO] [stdout] time-only search should not be capped at the default 100 iterations
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x6524456a7788 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x6524456a7788 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized::<std[d054f6f42beb1baa]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x6524456a7788 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x6524456a7788 - <<std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x6524456bdd9a - <core[5a1c3e9896636f3a]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x6524456bdd9a - core[5a1c3e9896636f3a]::fmt::write
[INFO] [stdout]    6:     0x6524456abfa2 - std[d054f6f42beb1baa]::io::default_write_fmt::<alloc[154f689e5dd3bae5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x6524456abfa2 - <alloc[154f689e5dd3bae5]::vec::Vec<u8> as std[d054f6f42beb1baa]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x652445686446 - <std[d054f6f42beb1baa]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x652445686446 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x65244569f9c9 - std[d054f6f42beb1baa]::panicking::default_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x6524455fba3c - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   12:     0x6524455fba3c - test[fad20673b750c10e]::test_main_inner::<test[fad20673b750c10e]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x65244569fb82 - <alloc[154f689e5dd3bae5]::boxed::Box<dyn for<'a, 'b> core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9
[INFO] [stdout]   14:     0x65244569fb82 - std[d054f6f42beb1baa]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x652445686534 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x65244567dd49 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace::<std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x65244568721d - __rustc[7ab284efd7f33ea8]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x6524456be52c - core[5a1c3e9896636f3a]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x6524455299ea - champions_engine[6fd98f4e115d56ec]::mcts::tests::time_only_budget_runs_without_iteration_cap
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mcts.rs:2683:9
[INFO] [stdout]   20:     0x6524455197f7 - champions_engine[6fd98f4e115d56ec]::mcts::tests::time_only_budget_runs_without_iteration_cap::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/mcts.rs:2667:53
[INFO] [stdout]   21:     0x65244532af26 - <champions_engine[6fd98f4e115d56ec]::mcts::tests::time_only_budget_runs_without_iteration_cap::{closure#0} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x6524455eeb1b - <fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x6524455eeb1b - test[fad20673b750c10e]::__rust_begin_short_backtrace::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18
[INFO] [stdout]   24:     0x6524455fc395 - test[fad20673b750c10e]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74
[INFO] [stdout]   25:     0x6524455fc395 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x6524455fc395 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x6524455fc395 - std[d054f6f42beb1baa]::panicking::catch_unwind::<core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x6524455fc395 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<test[fad20673b750c10e]::run_test_in_process::{closure#0}>, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x6524455fc395 - test[fad20673b750c10e]::run_test_in_process
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27
[INFO] [stdout]   30:     0x6524455fc395 - test[fad20673b750c10e]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43
[INFO] [stdout]   31:     0x6524455f6ef4 - test[fad20673b750c10e]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41
[INFO] [stdout]   32:     0x6524455f6ef4 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace::<test[fad20673b750c10e]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x6524455ff412 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x6524455ff412 - <core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x6524455ff412 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x6524455ff412 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x6524455ff412 - std[d054f6f42beb1baa]::panic::catch_unwind::<core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe<std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x6524455ff412 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x6524455ff412 - <std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked<test[fad20673b750c10e]::run_test::{closure#1}, ()>::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x6524456a6daf - <alloc[154f689e5dd3bae5]::boxed::Box<dyn core[5a1c3e9896636f3a]::ops::function::FnOnce<(), Output = ()> + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9
[INFO] [stdout]   41:     0x6524456a6daf - <std[d054f6f42beb1baa]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x7ffabbc43aa4 - <unknown>
[INFO] [stdout]   43:     0x7ffabbcd0a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     mcts::tests::time_only_budget_runs_without_iteration_cap
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 154 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.21s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "0a84a9d775eba306e0ed8a7ec5766da7613b3e208df24b818f44e9020a355a98", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0a84a9d775eba306e0ed8a7ec5766da7613b3e208df24b818f44e9020a355a98", kill_on_drop: false }`
[INFO] [stdout] 0a84a9d775eba306e0ed8a7ec5766da7613b3e208df24b818f44e9020a355a98
